[INFO] fetching crate nutrition_rs 0.2.0...
[INFO] testing nutrition_rs-0.2.0 against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065-1
[INFO] extracting crate nutrition_rs 0.2.0 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate nutrition_rs 0.2.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate nutrition_rs 0.2.0
[INFO] tweaked toml for crates.io crate nutrition_rs 0.2.0 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate nutrition_rs 0.2.0 on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate nutrition_rs 0.2.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded logos v0.16.0
[INFO] [stderr]   Downloaded logos-derive v0.16.0
[INFO] [stderr]   Downloaded clap_lex v0.7.7
[INFO] [stderr]   Downloaded beef v0.5.2
[INFO] [stderr]   Downloaded async-openai-macros v0.1.1
[INFO] [stderr]   Downloaded eventsource-stream v0.2.3
[INFO] [stderr]   Downloaded secrecy v0.10.3
[INFO] [stderr]   Downloaded schemars_derive v1.2.0
[INFO] [stderr]   Downloaded ariadne v0.4.1
[INFO] [stderr]   Downloaded ar_archive_writer v0.2.0
[INFO] [stderr]   Downloaded logos-codegen v0.16.0
[INFO] [stderr]   Downloaded security-framework v3.5.1
[INFO] [stderr]   Downloaded schemars v1.2.0
[INFO] [stderr]   Downloaded stacker v0.1.22
[INFO] [stderr]   Downloaded cc v1.2.53
[INFO] [stderr]   Downloaded backoff v0.4.0
[INFO] [stderr]   Downloaded wasm-bindgen-futures v0.4.58
[INFO] [stderr]   Downloaded reqwest-eventsource v0.6.0
[INFO] [stderr]   Downloaded async-openai v0.32.3
[INFO] [stderr]   Downloaded chumsky v0.12.0
[INFO] [stderr]   Downloaded minijinja v2.16.0
[INFO] [stderr]   Downloaded unicode-width v0.1.14
[INFO] [stderr]   Downloaded find-msvc-tools v0.1.8
[INFO] [stderr]   Downloaded object v0.32.2
[INFO] [stderr]   Downloaded psm v0.1.28
[INFO] [stderr]   Downloaded regex-syntax v0.7.5
[INFO] [stderr]   Downloaded zmij v1.0.16
[INFO] [stderr]   Downloaded web-sys v0.3.85
[INFO] [stderr]   Downloaded regex-automata v0.3.9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 90af1930c36a031fa7309e1dea85eb9d061bc15175b3e997762689eb02e46a3c
[INFO] running `Command { std: "docker" "start" "-a" "90af1930c36a031fa7309e1dea85eb9d061bc15175b3e997762689eb02e46a3c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "90af1930c36a031fa7309e1dea85eb9d061bc15175b3e997762689eb02e46a3c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "90af1930c36a031fa7309e1dea85eb9d061bc15175b3e997762689eb02e46a3c", kill_on_drop: false }`
[INFO] [stdout] 90af1930c36a031fa7309e1dea85eb9d061bc15175b3e997762689eb02e46a3c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] dacab25bd9ce82d648a86c5ff6009ddb8428b8ab5fbeb82df335579903151c97
[INFO] running `Command { std: "docker" "start" "-a" "dacab25bd9ce82d648a86c5ff6009ddb8428b8ab5fbeb82df335579903151c97", kill_on_drop: false }`
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling quote v1.0.43
[INFO] [stderr]    Compiling libc v0.2.180
[INFO] [stderr]    Compiling find-msvc-tools v0.1.8
[INFO] [stderr]    Compiling bytes v1.11.0
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling cc v1.2.53
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling syn v2.0.114
[INFO] [stderr]    Compiling slab v0.4.11
[INFO] [stderr]    Compiling futures-io v0.3.31
[INFO] [stderr]    Compiling tracing-core v0.1.36
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling zerocopy v0.8.33
[INFO] [stderr]    Compiling zmij v1.0.16
[INFO] [stderr]    Compiling socket2 v0.6.1
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling getrandom v0.2.17
[INFO] [stderr]    Compiling ring v0.17.14
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling sync_wrapper v1.0.2
[INFO] [stderr]    Compiling rustls v0.23.36
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling ident_case v1.0.1
[INFO] [stderr]    Compiling httpdate v1.0.3
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling object v0.32.2
[INFO] [stderr]    Compiling ipnet v2.11.0
[INFO] [stderr]    Compiling unicase v2.9.0
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling mime_guess v2.0.5
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling ryu v1.0.22
[INFO] [stderr]    Compiling rustls-native-certs v0.8.3
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling iri-string v0.7.10
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling minimal-lexical v0.2.1
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling darling_core v0.20.11
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling ar_archive_writer v0.2.0
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling rustls-webpki v0.103.9
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling psm v0.1.28
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling darling_macro v0.20.11
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling darling v0.20.11
[INFO] [stderr]    Compiling derive_builder_core v0.20.2
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling icu_properties v2.1.2
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling stacker v0.1.22
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling ref-cast v1.0.25
[INFO] [stderr]    Compiling beef v0.5.2
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling logos-codegen v0.16.0
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling derive_builder_macro v0.20.2
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling ref-cast-impl v1.0.25
[INFO] [stderr]    Compiling url v2.5.8
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling eventsource-stream v0.2.3
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling serde_derive_internals v0.29.1
[INFO] [stderr]    Compiling instant v0.1.13
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling futures-timer v3.0.3
[INFO] [stderr]    Compiling clap_lex v0.7.7
[INFO] [stderr]    Compiling hyper-util v0.1.19
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling allocator-api2 v0.2.21
[INFO] [stderr]    Compiling foldhash v0.1.5
[INFO] [stderr]    Compiling clap_derive v4.5.49
[INFO] [stderr]    Compiling clap_builder v4.5.54
[INFO] [stderr]    Compiling schemars_derive v1.2.0
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling backoff v0.4.0
[INFO] [stderr]    Compiling logos-derive v0.16.0
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling secrecy v0.10.3
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling derive_builder v0.20.2
[INFO] [stderr]    Compiling axum-core v0.5.6
[INFO] [stderr]    Compiling async-openai-macros v0.1.1
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling serde_path_to_error v0.1.20
[INFO] [stderr]    Compiling unicode-width v0.1.14
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling matchit v0.8.4
[INFO] [stderr]    Compiling unicode-segmentation v1.12.0
[INFO] [stderr]    Compiling ariadne v0.4.1
[INFO] [stderr]    Compiling clap v4.5.54
[INFO] [stderr]    Compiling schemars v1.2.0
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling chumsky v0.12.0
[INFO] [stderr]    Compiling logos v0.16.0
[INFO] [stderr]    Compiling minijinja v2.16.0
[INFO] [stderr]    Compiling async-trait v0.1.89
[INFO] [stderr]    Compiling axum v0.8.8
[INFO] [stderr]    Compiling reqwest-eventsource v0.6.0
[INFO] [stderr]    Compiling async-openai v0.32.3
[INFO] [stderr]    Compiling nutrition_rs v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 2m 56s
[INFO] running `Command { std: "docker" "inspect" "dacab25bd9ce82d648a86c5ff6009ddb8428b8ab5fbeb82df335579903151c97", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dacab25bd9ce82d648a86c5ff6009ddb8428b8ab5fbeb82df335579903151c97", kill_on_drop: false }`
[INFO] [stdout] dacab25bd9ce82d648a86c5ff6009ddb8428b8ab5fbeb82df335579903151c97
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 896f693f86b338619bc0a1012f68593b13bab97eaa659937deca403a9a17257a
[INFO] running `Command { std: "docker" "start" "-a" "896f693f86b338619bc0a1012f68593b13bab97eaa659937deca403a9a17257a", kill_on_drop: false }`
[INFO] [stderr]    Compiling tokio v1.49.0
[INFO] [stderr]    Compiling tower v0.4.13
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling tower v0.5.3
[INFO] [stderr]    Compiling tokio-rustls v0.26.4
[INFO] [stderr]    Compiling tokio-util v0.7.18
[INFO] [stderr]    Compiling tokio-stream v0.1.18
[INFO] [stderr]    Compiling backoff v0.4.0
[INFO] [stderr]    Compiling tower-http v0.6.8
[INFO] [stderr]    Compiling hyper-util v0.1.19
[INFO] [stderr]    Compiling hyper-rustls v0.27.7
[INFO] [stderr]    Compiling axum v0.8.8
[INFO] [stderr]    Compiling reqwest v0.12.28
[INFO] [stderr]    Compiling reqwest-eventsource v0.6.0
[INFO] [stderr]    Compiling async-openai v0.32.3
[INFO] [stderr]    Compiling nutrition_rs v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 14s
[INFO] running `Command { std: "docker" "inspect" "896f693f86b338619bc0a1012f68593b13bab97eaa659937deca403a9a17257a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "896f693f86b338619bc0a1012f68593b13bab97eaa659937deca403a9a17257a", kill_on_drop: false }`
[INFO] [stdout] 896f693f86b338619bc0a1012f68593b13bab97eaa659937deca403a9a17257a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7af35210897eee1c6ef7ef6d2589a3d703b9016d0e1ead4af1f0ab741fdb9355
[INFO] running `Command { std: "docker" "start" "-a" "7af35210897eee1c6ef7ef6d2589a3d703b9016d0e1ead4af1f0ab741fdb9355", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.40s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/nutrition_rs-31eefba0ed2554fd)
[INFO] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test cli::generate::recipe::tests::cook_line_without_quantity_is_ignored ... ok
[INFO] [stdout] test cli::tests::report_mode_rejects_mixing_date_and_range_flags ... ok
[INFO] [stdout] test cli::generate::recipe::tests::cook_line_with_multiple_measurements_keeps_first_unit ... ok
[INFO] [stdout] test cli::generate::recipe::tests::cook_aisle_headers_are_ignored_in_full_input ... ok
[INFO] [stdout] test cli::generate::recipe::tests::cook_section_header_is_ignored ... ok
[INFO] [stdout] test cli::generate::recipe::tests::cook_line_with_extra_numeric_segments_is_still_parseable ... ok
[INFO] [stdout] test cli::tests::report_mode_defaults_to_single_today ... ok
[INFO] [stdout] test cli::tests::report_mode_supports_range_with_partial_bounds ... ok
[INFO] [stdout] test cli::tests::report_mode_uses_positional_date ... ok
[INFO] [stdout] test display::tests::format_daily_report_omits_exercise_section_when_empty ... ok
[INFO] [stdout] test display::tests::all_rows_have_same_display_width ... ok
[INFO] [stdout] test display::tests::format_daily_report_shows_all_sections ... ok
[INFO] [stdout] test display::tests::format_nutrition_report_contains_header_and_properties ... ok
[INFO] [stdout] test emitters::day::tests::test_day_emitter ... ok
[INFO] [stdout] test cli::validate::tests::semantic_validate_reports_unknown_day_exercised_alias ... ok
[INFO] [stdout] test cli::validate::tests::semantic_validate_allows_resolved_references ... ok
[INFO] [stdout] test emitters::exercise::tests::emit_exercise_without_properties ... ok
[INFO] [stdout] test nutrition_units::tests::add_incompatible_units_returns_error ... ok
[INFO] [stdout] test cli::validate::tests::semantic_validate_reports_unknown_day_ate_alias ... ok
[INFO] [stdout] test cli::validate::tests::semantic_validate_allows_resolved_references_case_insensitively ... ok
[INFO] [stdout] test cli::validate::tests::semantic_validate_reports_unknown_recipe_ingredient_alias ... ok
[INFO] [stdout] test display::tests::format_nutrition_report_no_properties_shows_placeholder ... ok
[INFO] [stdout] test nutrition_units::tests::add_same_units ... ok
[INFO] [stdout] test nutrition_units::tests::convert_same_unit_is_identity ... ok
[INFO] [stdout] test nutrition_units::tests::convert_unknown_unit_returns_none ... ok
[INFO] [stdout] test nutrition_units::tests::default_units_case_insensitive ... ok
[INFO] [stdout] test nutrition_units::tests::default_units_for_common_properties ... ok
[INFO] [stdout] test nutrition_units::tests::add_with_ingredient_scoped_equivalency ... ok
[INFO] [stdout] test nutrition_units::tests::ingredient_scoped_equivalency_100g_equals_1cup ... ok
[INFO] [stdout] test nutrition_units::tests::si_energy_conversions ... ok
[INFO] [stdout] test nutrition_units::tests::multihop_conversion_mg_to_kg ... ok
[INFO] [stdout] test nutrition_units::tests::nutrition_quantity_display ... ok
[INFO] [stdout] test nutrition_units::tests::si_mass_conversions ... ok
[INFO] [stdout] test nutrition_units::tests::si_volume_conversions ... ok
[INFO] [stdout] test nutrition_units::tests::ingredient_scoped_equivalency_1pie_equals_8slices ... ok
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/nutrition-775568d0a375172f)
[INFO] [stdout] test cli::generate::recipe::tests::cook_line_with_simple_quantity_parses ... ok
[INFO] [stdout] test emitters::exercise::tests::emit_exercise_with_properties ... ok
[INFO] [stdout] test nutrition_units::tests::add_with_si_conversion ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/emitter_day.rs (/opt/rustwide/target/debug/deps/emitter_day-f04cec40b1b963c5)
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test emitter_and_to_string_agree_on_meal_label_syntax ... ok
[INFO] [stdout] test emitter_consecutive_meal_labels_roundtrip ... ok
[INFO] [stdout] test emitter_meal_label_roundtrip ... ok
[INFO] [stdout] test emitter_emits_single_meal_label ... ok
[INFO] [stdout] test emitter_no_items_roundtrip ... ok
[INFO] [stdout] test emitter_preserves_meal_label_order_with_exercised ... ok
[INFO] [stdout] test to_string_meal_label_roundtrip ... ok
[INFO] [stdout] test emitter_meal_label_with_spaces_roundtrip ... ok
[INFO] [stdout] test emitter_preserves_meal_label_order_between_ate ... ok
[INFO] [stdout] test to_string_emits_meal_label_with_brackets ... ok
[INFO] [stdout] 
[INFO] [stderr]      Running tests/emitter_ingredient.rs (/opt/rustwide/target/debug/deps/emitter_ingredient-e52eaeb05f5d9a56)
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_emit_ingredient_with_properties ... ok
[INFO] [stderr]      Running tests/emitter_recipe.rs (/opt/rustwide/target/debug/deps/emitter_recipe-86ff835fa987cb96)
[INFO] [stdout] test test_emit_ingredient_without_properties ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test test_emit_recipe_with_ingredients ... ok
[INFO] [stderr]      Running tests/imports.rs (/opt/rustwide/target/debug/deps/imports-ea251b27ce21dbba)
[INFO] [stdout] test test_emit_recipe_without_ingredients ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test load_tree_reports_cycle_for_recursive_imports ... ok
[INFO] [stdout] test load_tree_resolves_recursive_imports ... ok
[INFO] [stderr]      Running tests/lexer.rs (/opt/rustwide/target/debug/deps/lexer-a04eed2e25e6368d)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 24 tests
[INFO] [stdout] test test_all_at_keywords ... ok
[INFO] [stdout] test test_booleans ... ok
[INFO] [stdout] test test_comment_with_special_chars ... ok
[INFO] [stdout] test test_comments ... ok
[INFO] [stdout] test test_floats ... ok
[INFO] [stdout] test test_identifiers ... ok
[INFO] [stdout] test test_ingredient_with_properties ... ok
[INFO] [stdout] test test_empty_input ... ok
[INFO] [stdout] test test_keywords ... ok
[INFO] [stdout] test test_meal_label_with_special_chars ... ok
[INFO] [stdout] test test_meal_with_items ... ok
[INFO] [stdout] test test_meal_labels ... ok
[INFO] [stdout] test test_numbers_with_leading_zero ... ok
[INFO] [stdout] test test_newlines ... ok
[INFO] [stdout] test test_only_newlines ... ok
[INFO] [stdout] test test_only_whitespace ... ok
[INFO] [stdout] test test_punctuation ... ok
[INFO] [stdout] test test_string_empty ... ok
[INFO] [stdout] test test_strings ... ok
[INFO] [stdout] test test_whitespace_is_skipped ... ok
[INFO] [stdout] test test_integers ... ok
[INFO] [stdout] test test_identifier_with_numbers ... ok
[INFO] [stdout] test test_strings_with_escapes ... ok
[INFO] [stdout] test test_lex_example_file ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 24 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.19s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/nutrition.rs (/opt/rustwide/target/debug/deps/nutrition-6bb3353c1148d22a)
[INFO] [stdout] 
[INFO] [stdout] running 25 tests
[INFO] [stdout] test compute_report_no_filter_returns_all_days ... ok
[INFO] [stdout] test daily_report_subtracts_exercise_calories ... ok
[INFO] [stdout] test aggregate_reports_single_day_returns_same_values ... ok
[INFO] [stdout] test compute_report_filters_by_date_range ... ok
[INFO] [stdout] test daily_report_resolves_ate_and_exercised_case_insensitively ... ok
[INFO] [stdout] test aggregate_reports_subtracts_exercise_in_net ... ok
[INFO] [stdout] test daily_report_unknown_food_skipped_gracefully ... ok
[INFO] [stdout] test daily_report_scales_recipe_servings_by_declared_yield ... ok
[INFO] [stdout] test daily_report_sums_ate_intake ... ok
[INFO] [stdout] test query_nutrition_unknown_alias_returns_error ... ok
[INFO] [stdout] test recipe_nutrition_sums_ingredient_properties ... ok
[INFO] [stdout] test aggregate_reports_averages_properties_across_days ... ok
[INFO] [stdout] test query_nutrition_matches_alias_case_insensitively ... ok
[INFO] [stdout] test recipe_nutrition_with_requested_quantity_scales_result ... ok
[INFO] [stdout] test nutrition_report_to_json_is_valid_json ... ok
[INFO] [stdout] test scale_ingredient_cross_unit_via_equivalency ... ok
[INFO] [stdout] test scale_ingredient_same_unit_doubles_properties ... ok
[INFO] [stdout] test query_nutrition_finds_ingredient ... ok
[INFO] [stdout] test scale_ingredient_no_quantity_is_identity ... ok
[INFO] [stdout] test query_nutrition_finds_recipe ... ok
[INFO] [stdout] test recipe_unknown_ingredient_returns_error ... ok
[INFO] [stdout] test trace_report_marks_unresolved_ate_alias ... ok
[INFO] [stdout] test trace_report_includes_recipe_children ... ok
[INFO] [stdout] test unitless_calories_and_kcal_exercise_produce_consistent_units ... ok
[INFO] [stdout] test unitless_calories_in_ingredient_are_normalised_to_kcal ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 25 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/parser.rs (/opt/rustwide/target/debug/deps/parser-dbbfa7f825c8311f)
[INFO] [stdout] 
[INFO] [stdout] running 35 tests
[INFO] [stdout] test diagnostic_day_block_note_span_within_source ... ok
[INFO] [stdout] test diagnostic_day_block_flags_unexpected_string ... ok
[INFO] [stdout] test diagnostic_ingredient_block_flags_unexpected_string ... ok
[INFO] [stdout] test diagnostic_header_only_when_no_brace ... ok
[INFO] [stdout] test diagnostic_header_flags_comma_separated_aliases ... ok
[INFO] [stdout] test diagnostics_empty_source_no_diagnostics ... ok
[INFO] [stdout] test diagnostics_carry_byte_span_into_source ... ok
[INFO] [stdout] test exercise_aliases_allow_newlines_and_comments_between_strings ... ok
[INFO] [stdout] test diagnostics_recover_valid_item_after_bad_one ... ok
[INFO] [stdout] test food_aliases_allow_newlines_and_comments_between_strings ... ok
[INFO] [stdout] test exercise_aliases_inline_and_newline_forms_are_equivalent ... ok
[INFO] [stdout] test food_aliases_inline_and_newline_forms_are_equivalent ... ok
[INFO] [stdout] test ingredient_aliases_inline_and_newline_forms_are_equivalent ... ok
[INFO] [stdout] test parse_ingredient_block_with_escaped_quotes ... ok
[INFO] [stdout] test parse_with_errors_empty_input_returns_empty_document ... ok
[INFO] [stdout] test parse_example_document ... ok
[INFO] [stdout] test parse_example_items_individually ... ok
[INFO] [stdout] test ingredient_aliases_allow_newlines_and_comments_between_strings ... ok
[INFO] [stdout] test parse_with_errors_error_messages_include_line_number ... ok
[INFO] [stdout] test parse_with_errors_returns_empty_errors_for_valid_input ... ok
[INFO] [stdout] test parse_with_errors_returns_error_for_invalid_input ... ok
[INFO] [stdout] test parse_with_errors_multiple_bad_items_all_reported ... ok
[INFO] [stdout] test parse_with_errors_recovers_valid_items_after_bad_one ... ok
[INFO] [stdout] test parses_basic_ingredient ... ok
[INFO] [stdout] test parses_comment_as_item ... ok
[INFO] [stdout] test parses_day_with_ate_and_exercised ... ok
[INFO] [stdout] test parses_exercise_block ... ok
[INFO] [stdout] test diagnostics_declaration_kind_matches_keyword ... ok
[INFO] [stdout] test diagnostics_empty_for_valid_source ... ok
[INFO] [stdout] test parses_import_as_item ... ok
[INFO] [stdout] test parses_import_followed_by_declaration ... ok
[INFO] [stdout] test recipe_aliases_allow_newlines_and_comments_between_strings ... ok
[INFO] [stdout] test parses_import_with_trailing_comment ... ok
[INFO] [stdout] test recipe_aliases_inline_and_newline_forms_are_equivalent ... ok
[INFO] [stdout] test parses_recipe_with_ingredient_labels ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 35 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/parser_day_blocks.rs (/opt/rustwide/target/debug/deps/parser_day_blocks-57a4873035e1de94)
[INFO] [stdout] 
[INFO] [stdout] running 31 tests
[INFO] [stdout] test parses_comments_only_between_all_items ... ok
[INFO] [stdout] test parses_ate_with_multi_word_unit ... ok
[INFO] [stdout] test parses_ate_and_exercised_mixed ... ok
[INFO] [stdout] test parses_comment_after_ate_before_meal_label ... ok
[INFO] [stdout] test parses_complex_day_with_all_elements ... ok
[INFO] [stdout] test parses_day_block_with_multiple_comments ... ok
[INFO] [stdout] test parses_day_block_with_multiple_meal_labels ... ok
[INFO] [stdout] test parses_comment_before_meal_label ... ok
[INFO] [stdout] test parses_day_block_with_single_meal_label ... ok
[INFO] [stdout] test parses_ate_without_explicit_quantity ... ok
[INFO] [stdout] test parses_day_block_with_only_comment ... ok
[INFO] [stdout] test parses_empty_day_block ... ok
[INFO] [stdout] test parses_many_ate_entries_in_one_meal ... ok
[INFO] [stdout] test parses_exercised_without_explicit_quantity ... ok
[INFO] [stdout] test parses_interleaved_everything ... ok
[INFO] [stdout] test parses_meal_label_with_comment_and_no_ate ... ok
[INFO] [stdout] test parses_meal_label_empty_then_another_with_ate ... ok
[INFO] [stdout] test parses_meal_label_with_spaces ... ok
[INFO] [stdout] test parses_meal_labels_back_to_back ... ok
[INFO] [stdout] test parses_day_block_with_only_newlines ... ok
[INFO] [stdout] test parses_multiple_ate_entries ... ok
[INFO] [stdout] test parses_multiple_exercised_entries ... ok
[INFO] [stdout] test parses_multiple_comments_between_items ... ok
[INFO] [stdout] test parses_multiple_meal_labels_with_ate_entries ... ok
[INFO] [stdout] test parses_meal_label_followed_by_comment ... ok
[INFO] [stdout] test parses_multiple_meal_labels_with_comments_between ... ok
[INFO] [stdout] test parses_single_ate_entry ... ok
[INFO] [stdout] test parses_meal_label_with_exercised ... ok
[INFO] [stdout] test parses_meal_label_with_comment_then_ate ... ok
[INFO] [stdout] test parses_meal_label_with_ate_entries ... ok
[INFO] [stdout] test parses_single_exercised_entry ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/semantic.rs (/opt/rustwide/target/debug/deps/semantic-5b7468cde99bacdf)
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test test_ate_reference ... ok
[INFO] [stdout] test test_complex_document_analysis ... ok
[INFO] [stdout] test test_day_parsing ... ok
[INFO] [stdout] test test_day_with_multiple_items ... ok
[INFO] [stdout] test test_exercised_entry ... ok
[INFO] [stdout] test test_ingredient_with_aliases ... ok
[INFO] [stdout] test test_fractional_quantities ... ok
[INFO] [stdout] test test_multiple_aliases_resolution ... ok
[INFO] [stdout] test test_quantity_parsing ... ok
[INFO] [stdout] test test_quantity_with_spaces ... ok
[INFO] [stdout] test test_parse_simple_ingredient ... ok
[INFO] [stdout] test test_recipe_with_ingredient_labels ... ok
[INFO] [stdout] test test_property_tracking ... ok
[INFO] [stdout] test test_semantic_analyzer_initialization ... ok
[INFO] [stdout] test test_recipe_ingredient_resolution ... ok
[INFO] [stdout] test test_semantic_analyzer_case_insensitive_alias_lookup ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tree_sitter.rs (/opt/rustwide/target/debug/deps/tree_sitter-636e247d78de816f)
[INFO] [stdout] 
[INFO] [stdout] running 15 tests
[INFO] [stdout] test test_comments_only ... ok
[INFO] [stdout] test test_empty_source ... ok
[INFO] [stdout] test test_invalid_syntax_returns_none ... ok
[INFO] [stdout] test test_parse_empty_ingredient ... ok
[INFO] [stdout] test test_parse_day_entry ... ok
[INFO] [stdout] test test_parse_ingredient_with_comments ... ok
[INFO] [stdout] test test_parse_example_file ... ok
[INFO] [stdout] test test_parse_multiple_entries ... ok
[INFO] [stdout] test test_parse_recipe ... ok
[INFO] [stdout] test test_parse_recipe_with_fractional_amount ... ok
[INFO] [stdout] test test_parse_day_with_exercise ... ok
[INFO] [stdout] test test_parse_ingredient_with_aliases ... ok
[INFO] [stdout] test test_parse_recipe_with_yield ... ok
[INFO] [stdout] test test_parse_simple_ingredient ... ok
[INFO] [stdout] test test_parse_with_various_units ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/units.rs (/opt/rustwide/target/debug/deps/units-c42b397ad97c9a3e)
[INFO] [stdout] 
[INFO] [stdout] running 12 tests
[INFO] [stdout] test req1_default_units_for_common_properties ... ok
[INFO] [stdout] test full_pipeline_chickpeas_ingredient ... ok
[INFO] [stdout] test full_pipeline_pizza_ingredient ... ok
[INFO] [stdout] test req1_parsed_properties_respect_declared_units ... ok
[INFO] [stdout] test req3_equivalency_100g_equals_1cup ... ok
[INFO] [stdout] test req4_cup_to_gram_for_chickpeas_does_not_hold_for_water ... ok
[INFO] [stdout] test req3_equivalency_1pie_equals_8slices ... ok
[INFO] [stdout] test req5_add_cups_and_grams_for_chickpeas ... ok
[INFO] [stderr]    Doc-tests nutrition_rs
[INFO] [stdout] test req5_add_incompatible_units_returns_error ... ok
[INFO] [stdout] test req5_add_slices_and_pies_for_pizza ... ok
[INFO] [stdout] test req2_custom_unit_slice_from_dsl ... ok
[INFO] [stdout] test req5_add_grams_and_kilograms_via_si ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test src/nutrition_units/mod.rs - nutrition_units::UnitRegistry (line 105) ... ok
[INFO] [stdout] test src/nutrition_units/mod.rs - nutrition_units::UnitRegistry::add (line 242) ... ok
[INFO] [stdout] test src/nutrition_units/mod.rs - nutrition_units::UnitRegistry::from_ingredient_quantities (line 180) ... ok
[INFO] [stdout] test src/nutrition_units/mod.rs - nutrition_units::NutritionQuantity (line 41) ... ok
[INFO] [stdout] test src/nutrition_units/mod.rs - nutrition_units::default_unit_for_property (line 20) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 1.71s; merged doctests compilation took 1.63s
[INFO] running `Command { std: "docker" "inspect" "7af35210897eee1c6ef7ef6d2589a3d703b9016d0e1ead4af1f0ab741fdb9355", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7af35210897eee1c6ef7ef6d2589a3d703b9016d0e1ead4af1f0ab741fdb9355", kill_on_drop: false }`
[INFO] [stdout] 7af35210897eee1c6ef7ef6d2589a3d703b9016d0e1ead4af1f0ab741fdb9355
